2012-03-20 12:20:20,538 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:20,539 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:20,539 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:20,541 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:20,544 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:20,544 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:20,549 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:20,568 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:20,569 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:20,572 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:20,575 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:20,578 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:20,580 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:20,628 - Created '20' parsers.
2012-03-20 12:20:20,642 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:20,642 - Velocimacro : Default library not found.
2012-03-20 12:20:20,642 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:20,642 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:20,642 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:20,643 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:20,884 - ResourceManager : found sql/base/Control.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:20,961 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:20,974 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:20,991 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,013 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,023 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,038 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,049 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,067 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,079 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,096 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,099 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,104 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,115 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,119 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,131 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,138 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,178 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,182 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,197 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,201 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,221 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,232 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,244 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,249 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,271 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,278 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,293 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,297 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,318 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,338 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,348 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,402 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,418 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,433 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,437 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,440 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,452 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,455 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,459 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,477 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,505 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,520 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,524 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,528 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,531 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,546 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,559 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,563 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,589 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,600 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,602 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,605 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,616 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,619 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,622 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,642 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,661 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,664 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,679 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,682 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,689 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,700 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,703 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,712 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,733 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,736 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,738 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,741 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,743 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,745 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,748 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,766 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,781 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,783 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,786 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,788 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,791 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,793 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,796 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,804 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,807 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,811 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,813 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,818 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,827 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,830 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,841 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,853 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,856 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,867 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,881 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,885 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,901 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,904 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,906 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,910 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,924 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,928 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,940 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:21,943 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:22,857 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:22,858 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:22,858 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:22,858 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:22,860 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:22,865 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:22,865 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:22,879 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:22,908 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:22,910 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:22,913 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:22,916 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:22,919 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:22,921 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:22,974 - Created '20' parsers.
2012-03-20 12:20:22,996 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:22,997 - Velocimacro : Default library not found.
2012-03-20 12:20:22,997 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:22,997 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:22,997 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:22,997 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:23,284 - ResourceManager : found sql/base/Control.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,329 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,341 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,348 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,358 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,372 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,377 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,387 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,397 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,408 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,412 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,420 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,436 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,440 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,443 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,446 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,468 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,489 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,502 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,512 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,526 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,541 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,553 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,557 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,581 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,619 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,628 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,633 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,637 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,640 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,643 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,647 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,652 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,681 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,684 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,687 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,691 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,694 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:23,695 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:23,695 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:23,695 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:23,697 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,697 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:23,700 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:23,700 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:23,704 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:23,704 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,713 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,721 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:23,723 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:23,726 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:23,727 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,729 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:23,733 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:23,735 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:23,744 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,754 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,765 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,778 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,781 - Created '20' parsers.
2012-03-20 12:20:23,781 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,786 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,797 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,799 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:23,801 - Velocimacro : Default library not found.
2012-03-20 12:20:23,801 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:23,801 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:23,801 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:23,801 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:23,802 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,819 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,826 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,829 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,833 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,843 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,846 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,857 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,869 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,877 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,889 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,892 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,903 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,907 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,916 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,918 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,928 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,937 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,940 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,942 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,944 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,947 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,949 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,952 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,970 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,984 - ResourceManager : found sql/base/postgresql/table.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,986 - ResourceManager : found sql/base/postgresql/drop.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,988 - ResourceManager : found sql/base/postgresql/sequence.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,991 - ResourceManager : found sql/base/postgresql/columns.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,993 - ResourceManager : found sql/base/postgresql/primarykey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,995 - ResourceManager : found sql/base/postgresql/unique.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:23,997 - ResourceManager : found sql/base/postgresql/index.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,006 - ResourceManager : found sql/base/postgresql/comment.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,011 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,014 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,017 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,022 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,032 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,040 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,042 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,052 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,062 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,071 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,081 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,095 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,098 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,118 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,121 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,130 - ResourceManager : found om/Control.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,132 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,138 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,142 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,160 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,162 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,162 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,162 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,162 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:24,163 - ResourceManager : found sql/base/postgresql/tablefk.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,168 - ResourceManager : found sql/base/postgresql/foreignkey.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,198 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:24,198 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:24,199 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:24,199 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:24,201 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:24,201 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:24,202 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:24,202 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:24,204 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:24,204 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:24,207 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:24,207 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:24,208 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:24,208 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:24,215 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:24,215 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:24,217 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:24,217 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:24,220 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:24,220 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:24,222 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:24,222 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:24,224 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:24,224 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:24,225 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:24,225 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:24,226 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:24,226 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:24,265 - Created '20' parsers.
2012-03-20 12:20:24,265 - Created '20' parsers.
2012-03-20 12:20:24,267 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:24,267 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:24,268 - Velocimacro : Default library not found.
2012-03-20 12:20:24,268 - Velocimacro : Default library not found.
2012-03-20 12:20:24,270 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:24,270 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:24,272 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:24,272 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:24,273 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:24,273 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:24,275 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:24,275 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:24,427 - ResourceManager : found om/ControlBase.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,427 - ResourceManager : found om/ControlBase.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,814 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,814 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,905 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:24,905 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:25,606 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:25,606 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:25,992 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:25,992 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:26,061 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:26,061 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:26,314 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:26,315 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:26,315 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:26,315 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:26,317 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:26,320 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:26,320 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:26,324 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:26,353 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:26,364 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:26,366 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:26,374 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:26,376 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:26,378 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:26,466 - Created '20' parsers.
2012-03-20 12:20:26,500 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:26,500 - Velocimacro : Default library not found.
2012-03-20 12:20:26,500 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:26,500 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:26,500 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:26,500 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:26,717 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:26,717 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:26,899 - ResourceManager : found om/Control.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,000 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,001 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,002 - RHS of #set statement is null. Context will not be modified. om/Control.vm [line 105, column 1]
2012-03-20 12:20:27,056 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:27,056 - Log4JLogChute initialized using file 'velocity.log'
2012-03-20 12:20:27,057 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:27,057 - Starting Apache Velocity v1.5 (compiled: 2007-02-22 08:52:29)
2012-03-20 12:20:27,059 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:27,059 - Default Properties File: org/apache/velocity/runtime/defaults/velocity.properties
2012-03-20 12:20:27,061 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:27,061 - Trying to use logger class org.apache.velocity.runtime.log.AvalonLogChute
2012-03-20 12:20:27,062 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:27,062 - Couldn't find class org.apache.velocity.runtime.log.AvalonLogChute or necessary supporting classes in classpath.
java.lang.NoClassDefFoundError: org/apache/log/format/Formatter
	at java.lang.Class.forName0(Native Method)
	at java.lang.Class.forName(Class.java:169)
	at org.apache.velocity.util.ClassUtils.getClass(ClassUtils.java:76)
	at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:95)
	at org.apache.velocity.runtime.log.LogManager.createLogChute(LogManager.java:147)
	at org.apache.velocity.runtime.log.LogManager.updateLog(LogManager.java:208)
	at org.apache.velocity.runtime.RuntimeInstance.initializeLog(RuntimeInstance.java:728)
	at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:240)
	at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:116)
	at org.apache.torque.task.TorqueDataModelTask.execute(TorqueDataModelTask.java:475)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
	at org.eclipse.ant.internal.launching.remote.EclipseSingleCheckExecutor.executeTargets(EclipseSingleCheckExecutor.java:30)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
	at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
	at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
	at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
	at org.apache.tools.ant.Task.perform(Task.java:348)
	at org.apache.tools.ant.Target.execute(Target.java:390)
	at org.apache.tools.ant.Target.performTasks(Target.java:411)
	at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
	at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
	at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
	at org.eclipse.ant.internal.launching.remote.EclipseDefaultExecutor.executeTargets(EclipseDefaultExecutor.java:32)
	at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.run(InternalAntRunner.java:424)
	at org.eclipse.ant.internal.launching.remote.InternalAntRunner.main(InternalAntRunner.java:138)
Caused by: java.lang.ClassNotFoundException: org.apache.log.format.Formatter
	at org.apache.tools.ant.AntClassLoader.findClassInComponents(AntClassLoader.java:1361)
	at org.apache.tools.ant.AntClassLoader.findClass(AntClassLoader.java:1311)
	at org.apache.tools.ant.AntClassLoader.loadClass(AntClassLoader.java:1064)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 53 more
2012-03-20 12:20:27,064 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:27,064 - Trying to use logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:27,066 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:27,066 - Using logger class org.apache.velocity.runtime.log.Log4JLogChute
2012-03-20 12:20:27,070 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:27,070 - Default ResourceManager initializing. (class org.apache.velocity.runtime.resource.ResourceManagerImpl)
2012-03-20 12:20:27,072 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:27,072 - ResourceCache: initialized (class org.apache.velocity.runtime.resource.ResourceCacheImpl)
2012-03-20 12:20:27,075 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:27,075 - Loaded System Directive: org.apache.velocity.runtime.directive.Literal
2012-03-20 12:20:27,077 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:27,077 - Loaded System Directive: org.apache.velocity.runtime.directive.Macro
2012-03-20 12:20:27,079 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:27,079 - Loaded System Directive: org.apache.velocity.runtime.directive.Parse
2012-03-20 12:20:27,082 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:27,082 - Loaded System Directive: org.apache.velocity.runtime.directive.Include
2012-03-20 12:20:27,084 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:27,084 - Loaded System Directive: org.apache.velocity.runtime.directive.Foreach
2012-03-20 12:20:27,088 - Created '20' parsers.
2012-03-20 12:20:27,088 - Created '20' parsers.
2012-03-20 12:20:27,090 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:27,090 - Velocimacro : "velocimacro.library" is not set.  Trying default library: VM_global_library.vm
2012-03-20 12:20:27,092 - Velocimacro : Default library not found.
2012-03-20 12:20:27,092 - Velocimacro : Default library not found.
2012-03-20 12:20:27,094 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:27,094 - Velocimacro : allowInline = true : VMs can be defined inline in templates
2012-03-20 12:20:27,096 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:27,096 - Velocimacro : allowInlineToOverride = false : VMs defined inline may NOT replace previous VM definitions
2012-03-20 12:20:27,097 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:27,097 - Velocimacro : allowInlineLocal = false : VMs defined inline will be global in scope if allowed.
2012-03-20 12:20:27,099 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:27,099 - Velocimacro : autoload off : VM system will not automatically reload global library macros
2012-03-20 12:20:27,161 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,161 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,220 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,220 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,314 - ResourceManager : found om/ControlBase.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,314 - ResourceManager : found om/ControlBase.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,562 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,562 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,623 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:27,623 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:27,627 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:27,627 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:27,810 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,810 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,846 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,846 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,864 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:27,864 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,029 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,029 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,173 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,173 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,401 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,401 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,425 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,425 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,643 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,643 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,651 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:28,651 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:28,683 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:28,683 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:28,685 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:28,685 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:28,790 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,790 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,836 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:28,836 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,054 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,054 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,092 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:29,092 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:29,094 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:29,094 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:29,168 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,168 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,202 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,202 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,230 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,230 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,524 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,524 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,557 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:29,557 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:29,566 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:29,566 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:29,686 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,686 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,725 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,725 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,755 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,755 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,858 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,858 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,925 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:29,925 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,086 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,086 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,148 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,148 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,334 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,334 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,360 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:30,360 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:30,380 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:30,380 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:30,393 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:30,393 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:30,493 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,493 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,548 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,548 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,748 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,748 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,802 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,802 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,809 - ResourceManager : found om/DatabaseMapInit.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:30,809 - ResourceManager : found om/DatabaseMapInit.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,159 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,159 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,209 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,209 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,582 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,582 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,634 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:31,634 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:31,644 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:31,644 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:31,813 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,813 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,865 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:31,865 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,020 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,020 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,133 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,133 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,162 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,162 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,318 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,318 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,326 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:32,326 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:32,338 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,338 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,351 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,351 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,411 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,411 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,437 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,437 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,545 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,545 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,576 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,576 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,578 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,578 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,659 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,659 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,686 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,686 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,843 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,843 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,870 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,870 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:32,881 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,881 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:32,963 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,963 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,988 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:32,988 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,103 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,103 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,204 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,204 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,239 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,239 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,353 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,353 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,366 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:33,366 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 365, column 1]
2012-03-20 12:20:33,374 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:33,374 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1901, column 1]
2012-03-20 12:20:33,385 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:33,385 - RHS of #set statement is null. Context will not be modified. om/Object.vm [line 1986, column 1]
2012-03-20 12:20:33,442 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,442 - ResourceManager : found om/Peer.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,476 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,476 - ResourceManager : found om/MapBuilder.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,584 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,584 - ResourceManager : found om/Object.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,615 - ResourceManager : found om/DatabaseMapInit.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:20:33,615 - ResourceManager : found om/DatabaseMapInit.vm with loader org.apache.velocity.runtime.resource.ResourceCacheImpl
2012-03-20 12:23:03,220 - Log4JLogChute initialized using file 'velocity.log'
